04-24 14:23:18 D/ModuleListener: ModuleListener.testStarted(com.google.android.assistant.tvts.AssistantPluginHandler#runAssistantFunctionalTests) on SKBFXYZO0C1V
04-24 14:23:18 D/NativeDevice: Using property ro.build.version.sdk=31 from cache.
04-24 14:23:18 D/DeviceHostUtils: apiLevel: 31
04-24 14:23:18 D/RunUtil: Running command null without timeout.
04-24 14:23:18 D/AppRunnerUtils: Checking service: com.google.android.katniss/.search.serviceapi.KatnissVoiceInteractionService
04-24 14:23:18 D/AppRunnerUtils: Running the following command: dumpsys activity service com.google.android.katniss/.search.serviceapi.KatnissVoiceInteractionService
04-24 14:23:18 D/RunUtil: Running command [adb, -s, SKBFXYZO0C1V, shell, dumpsys, activity, service, com.google.android.katniss/.search.serviceapi.KatnissVoiceInteractionService] with timeout: 2m 0s
04-24 14:23:18 I/AppRunnerUtils: Service PID = 12796
04-24 14:23:18 D/RunUtil: Running command null without timeout.
04-24 14:23:18 D/AppRunnerUtils: Checking service: com.google.android.katniss/.search.serviceapi.KatnissVoiceInteractionService
04-24 14:23:18 D/AppRunnerUtils: Running the following command: dumpsys activity service com.google.android.katniss/.search.serviceapi.KatnissVoiceInteractionService
04-24 14:23:18 D/RunUtil: Running command [adb, -s, SKBFXYZO0C1V, shell, dumpsys, activity, service, com.google.android.katniss/.search.serviceapi.KatnissVoiceInteractionService] with timeout: 2m 0s
04-24 14:23:18 I/AppRunnerUtils: Service PID = 12796
04-24 14:23:18 D/AppRunnerUtils: Running the following command: am start --es query Weather -p com.google.android.katniss -c android.intent.category.DEFAULT -a android.intent.action.ASSIST
04-24 14:23:18 D/RunUtil: Running command [adb, -s, SKBFXYZO0C1V, shell, am, start, --es, query, Weather, -p, com.google.android.katniss, -c, android.intent.category.DEFAULT, -a, android.intent.action.ASSIST] with timeout: 2m 0s
04-24 14:23:19 I/NativeDeviceStateMonitor: Device SKBFXYZO0C1V is already ONLINE
04-24 14:23:19 I/NativeDeviceStateMonitor: Waiting 360000 ms for device SKBFXYZO0C1V boot complete
04-24 14:23:19 I/DeviceStateMonitor: Waiting 359928 ms for device SKBFXYZO0C1V package manager
04-24 14:23:19 I/NativeDeviceStateMonitor: Waiting 359816 ms for device SKBFXYZO0C1V external store
04-24 14:23:22 D/AppRunnerUtils: foregroundActivitySet(): [com.google.android.katniss/com.google.android.apps.tvsearch.results.activity.SearchResultActivity]
04-24 14:23:22 D/AppRunnerUtils: getActivityShownByPackage(): ActivityName: com.google.android.apps.tvsearch.results.activity.SearchResultActivity.
04-24 14:23:22 D/AssistantTestUtils: Assistant successfully launched: true
04-24 14:23:23 D/AppRunnerUtils: Running the following command: am force-stop com.google.android.katniss
04-24 14:23:23 D/RunUtil: Running command [adb, -s, SKBFXYZO0C1V, shell, am, force-stop, com.google.android.katniss] with timeout: 2m 0s
04-24 14:23:24 D/NativeDevice: Using property ro.build.version.sdk=31 from cache.
04-24 14:23:24 D/NativeDevice: Using property ro.build.version.sdk=31 from cache.
04-24 14:23:24 D/NativeDevice: Using property ro.build.version.sdk=31 from cache.
04-24 14:23:24 D/NativeDevice: Using property ro.build.version.sdk=31 from cache.
04-24 14:23:24 D/RunUtil: Running command null without timeout.
04-24 14:23:24 D/AppRunnerUtils: Checking service: com.google.android.katniss/.search.serviceapi.KatnissVoiceInteractionService
04-24 14:23:24 D/AppRunnerUtils: Running the following command: dumpsys activity service com.google.android.katniss/.search.serviceapi.KatnissVoiceInteractionService
04-24 14:23:24 D/RunUtil: Running command [adb, -s, SKBFXYZO0C1V, shell, dumpsys, activity, service, com.google.android.katniss/.search.serviceapi.KatnissVoiceInteractionService] with timeout: 2m 0s
04-24 14:23:24 I/AppRunnerUtils: Service PID = 13239
04-24 14:23:24 D/RunUtil: Running command null without timeout.
04-24 14:23:24 D/AppRunnerUtils: Checking service: com.google.android.katniss/.search.serviceapi.KatnissVoiceInteractionService
04-24 14:23:24 D/AppRunnerUtils: Running the following command: dumpsys activity service com.google.android.katniss/.search.serviceapi.KatnissVoiceInteractionService
04-24 14:23:24 D/RunUtil: Running command [adb, -s, SKBFXYZO0C1V, shell, dumpsys, activity, service, com.google.android.katniss/.search.serviceapi.KatnissVoiceInteractionService] with timeout: 2m 0s
04-24 14:23:24 I/AppRunnerUtils: Service PID = 13239
04-24 14:23:24 I/AssistantTestUtils: Waiting for assistant to be ready...
04-24 14:23:24 D/AppRunnerUtils: Running the following command: am start --es query Weather -p com.google.android.katniss -c android.intent.category.DEFAULT -a android.intent.action.ASSIST
04-24 14:23:24 D/RunUtil: Running command [adb, -s, SKBFXYZO0C1V, shell, am, start, --es, query, Weather, -p, com.google.android.katniss, -c, android.intent.category.DEFAULT, -a, android.intent.action.ASSIST] with timeout: 2m 0s
04-24 14:23:25 I/NativeDeviceStateMonitor: Device SKBFXYZO0C1V is already ONLINE
04-24 14:23:25 I/NativeDeviceStateMonitor: Waiting 360000 ms for device SKBFXYZO0C1V boot complete
04-24 14:23:25 I/DeviceStateMonitor: Waiting 359897 ms for device SKBFXYZO0C1V package manager
04-24 14:23:25 I/NativeDeviceStateMonitor: Waiting 359770 ms for device SKBFXYZO0C1V external store
04-24 14:23:28 D/AppRunnerUtils: foregroundActivitySet(): [com.google.android.katniss/com.google.android.apps.tvsearch.results.activity.SearchResultActivity]
04-24 14:23:29 D/AppRunnerUtils: getActivityShownByPackage(): ActivityName: com.google.android.apps.tvsearch.results.activity.SearchResultActivity.
04-24 14:23:29 D/AssistantTestUtils: Assistant successfully launched: true
04-24 14:23:29 D/RunUtil: Running command [logcat -d -T 1713936202.000 | grep -E 'AssistantWrapper(Impl)?: Assistant is now running.'] without timeout.
04-24 14:23:29 I/AssistantTestUtils: Assistant ready: true
04-24 14:23:29 D/AppRunnerUtils: Running the following command: am start --es query Weather -p com.google.android.katniss -c android.intent.category.DEFAULT -a android.intent.action.ASSIST
04-24 14:23:29 D/RunUtil: Running command [adb, -s, SKBFXYZO0C1V, shell, am, start, --es, query, Weather, -p, com.google.android.katniss, -c, android.intent.category.DEFAULT, -a, android.intent.action.ASSIST] with timeout: 2m 0s
04-24 14:23:30 I/NativeDeviceStateMonitor: Device SKBFXYZO0C1V is already ONLINE
04-24 14:23:30 I/NativeDeviceStateMonitor: Waiting 359999 ms for device SKBFXYZO0C1V boot complete
04-24 14:23:30 I/DeviceStateMonitor: Waiting 359933 ms for device SKBFXYZO0C1V package manager
04-24 14:23:30 I/NativeDeviceStateMonitor: Waiting 359846 ms for device SKBFXYZO0C1V external store
04-24 14:23:32 D/AppRunnerUtils: foregroundActivitySet(): [com.google.android.katniss/com.google.android.apps.tvsearch.results.activity.SearchResultActivity]
04-24 14:23:33 D/AppRunnerUtils: getActivityShownByPackage(): ActivityName: com.google.android.apps.tvsearch.results.activity.SearchResultActivity.
04-24 14:23:33 D/AssistantTestUtils: Assistant successfully launched: true
04-24 14:23:33 I/KeyCodeUtils: Sending keyevent KEYCODE_BACK - intValue: 4
04-24 14:23:34 D/AppRunnerUtils: foregroundActivitySet(): [com.skb.tv/com.skb.google.tv.main.MainActivity]
04-24 14:23:35 D/AppRunnerUtils: getActivityShownByPackage(): ActivityName: com.skb.google.tv.main.MainActivity.
04-24 14:23:35 D/AppRunnerUtils: Running the following command: am start --es query Weather -p com.google.android.katniss -c android.intent.category.DEFAULT -a android.intent.action.ASSIST
04-24 14:23:35 D/RunUtil: Running command [adb, -s, SKBFXYZO0C1V, shell, am, start, --es, query, Weather, -p, com.google.android.katniss, -c, android.intent.category.DEFAULT, -a, android.intent.action.ASSIST] with timeout: 2m 0s
04-24 14:23:36 I/NativeDeviceStateMonitor: Device SKBFXYZO0C1V is already ONLINE
04-24 14:23:36 I/NativeDeviceStateMonitor: Waiting 360000 ms for device SKBFXYZO0C1V boot complete
04-24 14:23:36 I/DeviceStateMonitor: Waiting 359932 ms for device SKBFXYZO0C1V package manager
04-24 14:23:36 I/NativeDeviceStateMonitor: Waiting 359829 ms for device SKBFXYZO0C1V external store
04-24 14:23:38 D/RunUtil: Running command [adb, -s, SKBFXYZO0C1V, shell, dumpsys, window, windows, --proto] with timeout: 2m 0s
04-24 14:23:38 D/AppRunnerUtils: com.google.android.katniss/com.google.android.apps.tvsearch.results.activity.SearchResultActivity
04-24 14:23:38 D/AppRunnerUtils: Running the following command: am start --es query Weather -p com.google.android.katniss -c android.intent.category.DEFAULT -a android.intent.action.ASSIST
04-24 14:23:38 D/RunUtil: Running command [adb, -s, SKBFXYZO0C1V, shell, am, start, --es, query, Weather, -p, com.google.android.katniss, -c, android.intent.category.DEFAULT, -a, android.intent.action.ASSIST] with timeout: 2m 0s
04-24 14:23:39 I/NativeDeviceStateMonitor: Device SKBFXYZO0C1V is already ONLINE
04-24 14:23:39 I/NativeDeviceStateMonitor: Waiting 360000 ms for device SKBFXYZO0C1V boot complete
04-24 14:23:39 I/DeviceStateMonitor: Waiting 359934 ms for device SKBFXYZO0C1V package manager
04-24 14:23:39 I/NativeDeviceStateMonitor: Waiting 359847 ms for device SKBFXYZO0C1V external store
04-24 14:23:41 D/RunUtil: Running command [adb, -s, SKBFXYZO0C1V, shell, dumpsys, window, windows, --proto] with timeout: 2m 0s
04-24 14:23:41 D/AppRunnerUtils: com.google.android.katniss/com.google.android.apps.tvsearch.results.activity.SearchResultActivity
04-24 14:23:41 D/AppRunnerUtils: Running the following command: am start --es query Weather -p com.google.android.katniss -c android.intent.category.DEFAULT -a android.intent.action.ASSIST
04-24 14:23:41 D/RunUtil: Running command [adb, -s, SKBFXYZO0C1V, shell, am, start, --es, query, Weather, -p, com.google.android.katniss, -c, android.intent.category.DEFAULT, -a, android.intent.action.ASSIST] with timeout: 2m 0s
04-24 14:23:42 I/NativeDeviceStateMonitor: Device SKBFXYZO0C1V is already ONLINE
04-24 14:23:42 I/NativeDeviceStateMonitor: Waiting 360000 ms for device SKBFXYZO0C1V boot complete
04-24 14:23:42 I/DeviceStateMonitor: Waiting 359932 ms for device SKBFXYZO0C1V package manager
04-24 14:23:42 I/NativeDeviceStateMonitor: Waiting 359865 ms for device SKBFXYZO0C1V external store
04-24 14:23:44 D/RunUtil: Running command [adb, -s, SKBFXYZO0C1V, shell, dumpsys, window, windows, --proto] with timeout: 2m 0s
04-24 14:23:44 D/AppRunnerUtils: com.google.android.katniss/com.google.android.apps.tvsearch.results.activity.SearchResultActivity
04-24 14:23:44 D/AppRunnerUtils: Running the following command: am start --es query Weather -p com.google.android.katniss -c android.intent.category.DEFAULT -a android.intent.action.ASSIST
04-24 14:23:44 D/RunUtil: Running command [adb, -s, SKBFXYZO0C1V, shell, am, start, --es, query, Weather, -p, com.google.android.katniss, -c, android.intent.category.DEFAULT, -a, android.intent.action.ASSIST] with timeout: 2m 0s
04-24 14:23:44 I/NativeDeviceStateMonitor: Device SKBFXYZO0C1V is already ONLINE
04-24 14:23:44 I/NativeDeviceStateMonitor: Waiting 359999 ms for device SKBFXYZO0C1V boot complete
04-24 14:23:45 I/DeviceStateMonitor: Waiting 359933 ms for device SKBFXYZO0C1V package manager
04-24 14:23:45 I/NativeDeviceStateMonitor: Waiting 359871 ms for device SKBFXYZO0C1V external store
04-24 14:23:47 D/RunUtil: Running command [adb, -s, SKBFXYZO0C1V, shell, dumpsys, window, windows, --proto] with timeout: 2m 0s
04-24 14:23:47 D/AppRunnerUtils: com.google.android.katniss/com.google.android.apps.tvsearch.results.activity.SearchResultActivity
04-24 14:23:47 D/AppRunnerUtils: Running the following command: am start --es query Weather -p com.google.android.katniss -c android.intent.category.DEFAULT -a android.intent.action.ASSIST
04-24 14:23:47 D/RunUtil: Running command [adb, -s, SKBFXYZO0C1V, shell, am, start, --es, query, Weather, -p, com.google.android.katniss, -c, android.intent.category.DEFAULT, -a, android.intent.action.ASSIST] with timeout: 2m 0s
04-24 14:23:48 I/NativeDeviceStateMonitor: Device SKBFXYZO0C1V is already ONLINE
04-24 14:23:48 I/NativeDeviceStateMonitor: Waiting 360000 ms for device SKBFXYZO0C1V boot complete
04-24 14:23:48 I/DeviceStateMonitor: Waiting 359959 ms for device SKBFXYZO0C1V package manager
04-24 14:23:48 I/NativeDeviceStateMonitor: Waiting 359871 ms for device SKBFXYZO0C1V external store
04-24 14:23:50 D/RunUtil: Running command [adb, -s, SKBFXYZO0C1V, shell, dumpsys, window, windows, --proto] with timeout: 2m 0s
04-24 14:23:50 D/AppRunnerUtils: com.google.android.katniss/com.google.android.apps.tvsearch.results.activity.SearchResultActivity
04-24 14:23:50 D/AppRunnerUtils: foregroundActivitySet(): [com.google.android.katniss/com.google.android.apps.tvsearch.results.activity.SearchResultActivity]
04-24 14:23:50 D/AppRunnerUtils: getActivityShownByPackage(): ActivityName: com.google.android.apps.tvsearch.results.activity.SearchResultActivity.
04-24 14:23:50 D/AssistantTestUtils: Assistant setup not triggered after 5 retries. Current activity: com.google.android.katniss/com.google.android.apps.tvsearch.results.activity.SearchResultActivity
04-24 14:23:50 I/AssistantTestUtils: Assistant OOBE skipping required: false
04-24 14:23:50 I/KeyCodeUtils: Sending keyevent KEYCODE_BACK - intValue: 4
04-24 14:23:51 D/AppRunnerUtils: foregroundActivitySet(): [com.skb.tv/com.skb.google.tv.main.MainActivity]
04-24 14:23:52 D/AppRunnerUtils: getActivityShownByPackage(): ActivityName: com.skb.google.tv.main.MainActivity.
04-24 14:24:11 D/AppRunnerUtils: Running the following command: am force-stop com.google.android.katniss
04-24 14:24:11 D/RunUtil: Running command [adb, -s, SKBFXYZO0C1V, shell, am, force-stop, com.google.android.katniss] with timeout: 2m 0s
04-24 14:24:12 D/NativeDevice: Using property ro.build.version.sdk=31 from cache.
04-24 14:24:12 D/NativeDevice: Using property ro.build.version.sdk=31 from cache.
04-24 14:24:12 D/NativeDevice: Using property ro.build.version.sdk=31 from cache.
04-24 14:24:12 D/NativeDevice: Using property ro.build.version.sdk=31 from cache.
04-24 14:24:12 D/PrettyTestEventLogger: 
==================== com.google.android.assistant.tvts.AssistantPluginHandler#runAssistantFunctionalTests ENDED: Wed Apr 24 14:24:12 KST 2024 ====================
